[INFO] cloning repository https://github.com/randoguyname/bitstream-autocorrelation
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/randoguyname/bitstream-autocorrelation" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Frandoguyname%2Fbitstream-autocorrelation", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Frandoguyname%2Fbitstream-autocorrelation'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] d64867144507333f08ff0fe0970850b5c0197f7f
[INFO] testing randoguyname/bitstream-autocorrelation against master#1f7f8ea0721a3b1eb73e6c6d25cccb371434b320 for pr-154065
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Frandoguyname%2Fbitstream-autocorrelation" "/workspace/builds/worker-7-tc1/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-7-tc1/source'...
[INFO] [stderr] done.
[INFO] started tweaking git repo https://github.com/randoguyname/bitstream-autocorrelation
[INFO] finished tweaking git repo https://github.com/randoguyname/bitstream-autocorrelation
[INFO] tweaked toml for git repo https://github.com/randoguyname/bitstream-autocorrelation written to /workspace/builds/worker-7-tc1/source/Cargo.toml
[INFO] validating manifest of git repo https://github.com/randoguyname/bitstream-autocorrelation on toolchain 1f7f8ea0721a3b1eb73e6c6d25cccb371434b320
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1f7f8ea0721a3b1eb73e6c6d25cccb371434b320" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate git repo https://github.com/randoguyname/bitstream-autocorrelation already has a lockfile, it will not be regenerated
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1f7f8ea0721a3b1eb73e6c6d25cccb371434b320" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Updating crates.io index
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded csv-core v0.1.13
[INFO] [stderr]   Downloaded minimp3-sys v0.3.2
[INFO] [stderr]   Downloaded creak v0.3.0
[INFO] [stderr]   Downloaded minimp3 v0.5.2
[INFO] [stderr]   Downloaded mach2 v0.5.0
[INFO] [stderr]   Downloaded objc2-core-audio-types v0.3.2
[INFO] [stderr]   Downloaded toml_parser v1.0.8+spec-1.1.0
[INFO] [stderr]   Downloaded objc2-core-audio v0.3.2
[INFO] [stderr]   Downloaded claxon v0.4.3
[INFO] [stderr]   Downloaded hound v3.5.1
[INFO] [stderr]   Downloaded alsa v0.10.0
[INFO] [stderr]   Downloaded toml_edit v0.23.10+spec-1.0.0
[INFO] [stderr]   Downloaded slice-ring-buffer v0.3.4
[INFO] [stderr]   Downloaded cpal v0.17.1
[INFO] [stderr]   Downloaded objc2-avf-audio v0.3.2
[INFO] [stderr]   Downloaded objc2-audio-toolbox v0.3.2
[INFO] [stderr]   Downloaded csv v1.4.0
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+1f7f8ea0721a3b1eb73e6c6d25cccb371434b320" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] eec8c5261148038911e5062b81e71a054d7563e2a66657445334b7790ecacb27
[INFO] running `Command { std: "docker" "start" "-a" "eec8c5261148038911e5062b81e71a054d7563e2a66657445334b7790ecacb27", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "eec8c5261148038911e5062b81e71a054d7563e2a66657445334b7790ecacb27", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "eec8c5261148038911e5062b81e71a054d7563e2a66657445334b7790ecacb27", kill_on_drop: false }`
[INFO] [stdout] eec8c5261148038911e5062b81e71a054d7563e2a66657445334b7790ecacb27
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+1f7f8ea0721a3b1eb73e6c6d25cccb371434b320" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 9619bb4db41ec37f1692dbc0966970cea1847309780093a7e928a9bf8c3c351b
[INFO] running `Command { std: "docker" "start" "-a" "9619bb4db41ec37f1692dbc0966970cea1847309780093a7e928a9bf8c3c351b", kill_on_drop: false }`
[INFO] [stderr]    Compiling num-traits v0.2.19
[INFO] [stderr]    Compiling tracing-core v0.1.36
[INFO] [stderr]    Compiling serde_core v1.0.228
[INFO] [stderr]    Compiling lazy_static v1.5.0
[INFO] [stderr]    Compiling memchr v2.8.0
[INFO] [stderr]    Compiling nu-ansi-term v0.50.3
[INFO] [stderr]    Compiling iana-time-zone v0.1.65
[INFO] [stderr]    Compiling smallvec v1.15.1
[INFO] [stderr]    Compiling syn v2.0.116
[INFO] [stderr]    Compiling thread_local v1.1.9
[INFO] [stderr]    Compiling sharded-slab v0.1.7
[INFO] [stderr]    Compiling tracing-log v0.2.0
[INFO] [stderr]    Compiling csv-core v0.1.13
[INFO] [stderr]    Compiling tracing-subscriber v0.3.22
[INFO] [stderr]    Compiling chrono v0.4.43
[INFO] [stderr]    Compiling csv v1.4.0
[INFO] [stderr]    Compiling tracing-attributes v0.1.31
[INFO] [stderr]    Compiling tracing v0.1.44
[INFO] [stderr]    Compiling bitstream-autocorrelation v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 12.31s
[INFO] running `Command { std: "docker" "inspect" "9619bb4db41ec37f1692dbc0966970cea1847309780093a7e928a9bf8c3c351b", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "9619bb4db41ec37f1692dbc0966970cea1847309780093a7e928a9bf8c3c351b", kill_on_drop: false }`
[INFO] [stdout] 9619bb4db41ec37f1692dbc0966970cea1847309780093a7e928a9bf8c3c351b
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+1f7f8ea0721a3b1eb73e6c6d25cccb371434b320" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] efcc0534a6a7eaae2a41fee54c5585716013cdef5f7b77567ffff8bca717c792
[INFO] running `Command { std: "docker" "start" "-a" "efcc0534a6a7eaae2a41fee54c5585716013cdef5f7b77567ffff8bca717c792", kill_on_drop: false }`
[INFO] [stderr]    Compiling libc v0.2.182
[INFO] [stderr]    Compiling thiserror v1.0.69
[INFO] [stderr]    Compiling alsa-sys v0.3.1
[INFO] [stderr]    Compiling tinyvec_macros v0.1.1
[INFO] [stderr]    Compiling minimp3-sys v0.3.2
[INFO] [stderr]    Compiling ogg v0.8.0
[INFO] [stderr]    Compiling cpal v0.17.1
[INFO] [stderr]    Compiling claxon v0.4.3
[INFO] [stderr]    Compiling hound v3.5.1
[INFO] [stderr]    Compiling syn v2.0.116
[INFO] [stderr]    Compiling tinyvec v1.10.0
[INFO] [stderr]    Compiling lewton v0.10.2
[INFO] [stderr]    Compiling parking_lot_core v0.9.12
[INFO] [stderr]    Compiling errno v0.3.14
[INFO] [stderr]    Compiling slice-ring-buffer v0.3.4
[INFO] [stderr]    Compiling mio v1.1.1
[INFO] [stderr]    Compiling socket2 v0.6.2
[INFO] [stderr]    Compiling signal-hook-registry v1.4.8
[INFO] [stderr]    Compiling parking_lot v0.12.5
[INFO] [stderr]    Compiling alsa v0.10.0
[INFO] [stderr]    Compiling thiserror-impl v1.0.69
[INFO] [stderr]    Compiling tracing-attributes v0.1.31
[INFO] [stderr]    Compiling tokio-macros v2.6.0
[INFO] [stderr]    Compiling tokio v1.49.0
[INFO] [stderr]    Compiling tracing v0.1.44
[INFO] [stderr]    Compiling minimp3 v0.5.2
[INFO] [stderr]    Compiling bitstream-autocorrelation v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]    Compiling creak v0.3.0
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 22.31s
[INFO] running `Command { std: "docker" "inspect" "efcc0534a6a7eaae2a41fee54c5585716013cdef5f7b77567ffff8bca717c792", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "efcc0534a6a7eaae2a41fee54c5585716013cdef5f7b77567ffff8bca717c792", kill_on_drop: false }`
[INFO] [stdout] efcc0534a6a7eaae2a41fee54c5585716013cdef5f7b77567ffff8bca717c792
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+1f7f8ea0721a3b1eb73e6c6d25cccb371434b320" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 478f21d14ea9643afc368f900808fc5bea048e16f188197fc0c5fc8b6930b48b
[INFO] running `Command { std: "docker" "start" "-a" "478f21d14ea9643afc368f900808fc5bea048e16f188197fc0c5fc8b6930b48b", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.15s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/bitstream_autocorrelation-ab3726960a4f26b0)
[INFO] [stdout] 
[INFO] [stdout] running 3 tests
[INFO] [stdout] [2m2026-03-27T19:02:56.969117Z[0m [32m INFO[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m test-files/test-246-guitar.mp3 has sample rate 44100
[INFO] [stdout] [2m2026-03-27T19:02:56.970756Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Failed to find frequency
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-03-27T19:02:56.971450Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 538 is a subharmonic of 80 (0.6435547 vs 0.64160156)
[INFO] [stdout] [2m2026-03-27T19:02:56.971889Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 76.89746 at 44100hZ = 573.49097hZ
[INFO] [stdout] [2m2026-03-27T19:02:56.971909Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Not long enough since shift to check for harmonics (0)
[INFO] [stdout] [2m2026-03-27T19:02:56.971934Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Failed to find frequency
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-03-27T19:02:56.972351Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 93 with 182 (0.0703125 vs 0.9453125)
[INFO] [stdout] [2m2026-03-27T19:02:56.972372Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 182 with 355 (0.9453125 vs 0.9921875)
[INFO] [stdout] [2m2026-03-27T19:02:56.972983Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 355.13217 at 44100hZ = 124.179115hZ
[INFO] [stdout] [2m2026-03-27T19:02:56.973006Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 0
[INFO] [stdout] [2m2026-03-27T19:02:56.973021Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 124.179115
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-03-27T19:02:56.973425Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 85 with 176 (0.05078125 vs 0.9667969)
[INFO] [stdout] [2m2026-03-27T19:02:56.973444Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 176 with 357 (0.9667969 vs 0.99121094)
[INFO] [stdout] [2m2026-03-27T19:02:56.973458Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 715 is a subharmonic of 357 (0.99316406 vs 0.99121094)
[INFO] [stdout] [2m2026-03-27T19:02:56.974310Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 357.63272 at 44100hZ = 123.31087hZ
[INFO] [stdout] [2m2026-03-27T19:02:56.974394Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 1
[INFO] [stdout] [2m2026-03-27T19:02:56.974415Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 123.31087
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-03-27T19:02:56.974720Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 358 is a subharmonic of 178 (0.98828125 vs 0.9824219)
[INFO] [stdout] [2m2026-03-27T19:02:56.974741Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 714 is a subharmonic of 178 (0.9892578 vs 0.98828125)
[INFO] [stdout] [2m2026-03-27T19:02:56.974771Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 357 is a subharmonic of 178 (0.9902344 vs 0.9892578)
[INFO] [stdout] [2m2026-03-27T19:02:56.975938Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 178.57811 at 44100hZ = 246.95076hZ
[INFO] [stdout] [2m2026-03-27T19:02:56.976105Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Not long enough since shift to check for harmonics (2)
[INFO] [stdout] [2m2026-03-27T19:02:56.976153Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Confident shift at 0.9902344
[INFO] [stdout] [2m2026-03-27T19:02:56.976170Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [124.179115, 123.31087, 246.95076]
[INFO] [stdout] [2m2026-03-27T19:02:56.976187Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 2
[INFO] [stdout] [2m2026-03-27T19:02:56.976198Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 124.179115
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-03-27T19:02:56.976596Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 221 is a subharmonic of 43 (0.50390625 vs 0.49609375)
[INFO] [stdout] [2m2026-03-27T19:02:56.976618Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 577 is a subharmonic of 43 (0.52441406 vs 0.50390625)
[INFO] [stdout] [2m2026-03-27T19:02:56.976633Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 934 is a subharmonic of 43 (0.53808594 vs 0.52441406)
[INFO] [stdout] [2m2026-03-27T19:02:56.976647Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 43 with 178 (0.53808594 vs 0.9892578)
[INFO] [stdout] [2m2026-03-27T19:02:56.976660Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 357 is a subharmonic of 178 (0.99316406 vs 0.9892578)
[INFO] [stdout] [2m2026-03-27T19:02:56.977241Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 178.53876 at 44100hZ = 247.00519hZ
[INFO] [stdout] [2m2026-03-27T19:02:56.977259Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Not long enough since shift to check for harmonics (3)
[INFO] [stdout] [2m2026-03-27T19:02:56.977271Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Confident shift at 0.99316406
[INFO] [stdout] [2m2026-03-27T19:02:56.977282Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [247.00519, 123.31087, 246.95076]
[INFO] [stdout] [2m2026-03-27T19:02:56.977295Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 3
[INFO] [stdout] [2m2026-03-27T19:02:56.977307Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 246.95076
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-03-27T19:02:56.977699Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 51 with 138 (0.40722656 vs 0.5644531)
[INFO] [stdout] [2m2026-03-27T19:02:56.977726Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 357 is a subharmonic of 179 (0.99121094 vs 0.98535156)
[INFO] [stderr] ALSA lib confmisc.c:855:(parse_card) cannot find card '0'
[INFO] [stdout] [2m2026-03-27T19:02:56.986374Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 178.62439 at 44100hZ = 246.88678hZ
[INFO] [stderr] ALSA lib conf.c:5204:(_snd_config_evaluate) function snd_func_card_inum returned error: No such file or directory
[INFO] [stdout] [2m2026-03-27T19:02:56.986417Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [247.00519, 246.88678, 246.95076]
[INFO] [stderr] ALSA lib confmisc.c:422:(snd_func_concat) error evaluating strings
[INFO] [stdout] [2m2026-03-27T19:02:56.986436Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 4
[INFO] [stderr] ALSA lib conf.c:5204:(_snd_config_evaluate) function snd_func_concat returned error: No such file or directory
[INFO] [stdout] [2m2026-03-27T19:02:56.986451Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 246.95076
[INFO] [stderr] ALSA lib confmisc.c:1342:(snd_func_refer) error evaluating name
[INFO] [stdout] 
[INFO] [stderr] ALSA lib conf.c:5204:(_snd_config_evaluate) function snd_func_refer returned error: No such file or directory
[INFO] [stdout] 
[INFO] [stderr] ALSA lib conf.c:5727:(snd_config_expand) Evaluate error: No such file or directory
[INFO] [stderr] ALSA lib pcm.c:2721:(snd_pcm_open_noupdate) Unknown PCM default
[INFO] [stdout] [2m2026-03-27T19:02:56.993156Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 52 with 150 (0.4140625 vs 0.6845703)
[INFO] [stdout] [2m2026-03-27T19:02:56.993218Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 358 is a subharmonic of 181 (0.9873047 vs 0.98046875)
[INFO] [stdout] [2m2026-03-27T19:02:56.993804Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 179.00691 at 44100hZ = 246.3592hZ
[INFO] [stdout] [2m2026-03-27T19:02:56.993823Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [247.00519, 246.88678, 246.3592]
[INFO] [stdout] [2m2026-03-27T19:02:56.993840Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 5
[INFO] [stdout] [2m2026-03-27T19:02:56.993852Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 246.88678
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] test tests::test_from_files ... FAILED
[INFO] [stdout] [2m2026-03-27T19:02:57.004213Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 70 with 149 (0.19726563 vs 0.6816406)
[INFO] [stdout] [2m2026-03-27T19:02:57.005273Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 179.07858 at 44100hZ = 246.2606hZ
[INFO] [stdout] [2m2026-03-27T19:02:57.005309Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [246.2606, 246.88678, 246.3592]
[INFO] [stdout] [2m2026-03-27T19:02:57.007128Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 6
[INFO] [stdout] [2m2026-03-27T19:02:57.007527Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 246.3592
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-03-27T19:02:57.008218Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 351 is a subharmonic of 171 (0.9394531 vs 0.92285156)
[INFO] [stdout] [2m2026-03-27T19:02:57.008794Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 171 with 179 (0.9394531 vs 0.9873047)
[INFO] [stdout] [2m2026-03-27T19:02:57.011298Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 178.34215 at 44100hZ = 247.2775hZ
[INFO] [stdout] [2m2026-03-27T19:02:57.011486Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [246.2606, 247.2775, 246.3592]
[INFO] [stdout] [2m2026-03-27T19:02:57.012317Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 7
[INFO] [stdout] [2m2026-03-27T19:02:57.012396Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 246.3592
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-03-27T19:02:57.013551Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 92 with 343 (0.13378906 vs 0.84472656)
[INFO] [stdout] [2m2026-03-27T19:02:57.013703Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 174 with 357 (0.95214844 vs 0.98339844)
[INFO] [stdout] [2m2026-03-27T19:02:57.014390Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 177.46011 at 44100hZ = 248.50655hZ
[INFO] [stdout] test tests::test_with_microphone ... FAILED
[INFO] [stdout] [2m2026-03-27T19:02:57.014540Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [246.2606, 247.2775, 248.50655]
[INFO] [stdout] [2m2026-03-27T19:02:57.015579Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 8
[INFO] [stdout] [2m2026-03-27T19:02:57.015948Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 247.2775
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-03-27T19:02:57.016568Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 357 is a subharmonic of 176 (0.9794922 vs 0.9609375)
[INFO] [stdout] [2m2026-03-27T19:02:57.016757Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 716 is a subharmonic of 176 (0.984375 vs 0.9794922)
[INFO] [stdout] [2m2026-03-27T19:02:57.016895Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 179 is a subharmonic of 176 (0.9863281 vs 0.984375)
[INFO] [stdout] [2m2026-03-27T19:02:57.017103Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 359 is a subharmonic of 176 (0.99121094 vs 0.9863281)
[INFO] [stdout] [2m2026-03-27T19:02:57.017844Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 179.48502 at 44100hZ = 245.70296hZ
[INFO] [stdout] [2m2026-03-27T19:02:57.019610Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [245.70296, 247.2775, 248.50655]
[INFO] [stdout] [2m2026-03-27T19:02:57.019721Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 9
[INFO] [stdout] [2m2026-03-27T19:02:57.019783Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 247.2775
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-03-27T19:02:57.021691Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 179.40694 at 44100hZ = 245.80989hZ
[INFO] [stdout] [2m2026-03-27T19:02:57.024004Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [245.70296, 245.80989, 248.50655]
[INFO] [stdout] [2m2026-03-27T19:02:57.024106Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 10
[INFO] [stdout] [2m2026-03-27T19:02:57.024142Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 245.80989
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-03-27T19:02:57.024487Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 84 with 181 (0.12402344 vs 0.9404297)
[INFO] [stdout] [2m2026-03-27T19:02:57.026038Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 178.7008 at 44100hZ = 246.7812hZ
[INFO] [stdout] [2m2026-03-27T19:02:57.026121Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [245.70296, 245.80989, 246.7812]
[INFO] [stdout] [2m2026-03-27T19:02:57.026164Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 11
[INFO] [stdout] [2m2026-03-27T19:02:57.026249Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 245.80989
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-03-27T19:02:57.026700Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 100 with 209 (0.2763672 vs 0.6455078)
[INFO] [stdout] [2m2026-03-27T19:02:57.028715Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 178.88342 at 44100hZ = 246.52927hZ
[INFO] [stdout] [2m2026-03-27T19:02:57.028801Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [246.52927, 245.80989, 246.7812]
[INFO] [stdout] [2m2026-03-27T19:02:57.028844Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 12
[INFO] [stdout] [2m2026-03-27T19:02:57.029209Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 246.52927
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-03-27T19:02:57.030093Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 538 is a subharmonic of 178 (0.9824219 vs 0.9824219)
[INFO] [stdout] [2m2026-03-27T19:02:57.030175Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 179 is a subharmonic of 178 (0.98339844 vs 0.9824219)
[INFO] [stdout] [2m2026-03-27T19:02:57.031015Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 180.69453 at 44100hZ = 244.05829hZ
[INFO] [stdout] [2m2026-03-27T19:02:57.031075Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [246.52927, 244.05829, 246.7812]
[INFO] [stdout] [2m2026-03-27T19:02:57.031114Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 13
[INFO] [stdout] [2m2026-03-27T19:02:57.031218Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 246.52927
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-03-27T19:02:57.031806Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 716 is a subharmonic of 179 (0.98046875 vs 0.98046875)
[INFO] [stdout] [2m2026-03-27T19:02:57.032216Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 179.33658 at 44100hZ = 245.90633hZ
[INFO] [stdout] [2m2026-03-27T19:02:57.032285Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [246.52927, 244.05829, 245.90633]
[INFO] [stdout] [2m2026-03-27T19:02:57.032330Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 14
[INFO] [stdout] [2m2026-03-27T19:02:57.032415Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 245.90633
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-03-27T19:02:57.032749Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 536 is a subharmonic of 179 (0.99316406 vs 0.99121094)
[INFO] [stdout] [2m2026-03-27T19:02:57.033157Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 179.20088 at 44100hZ = 246.09254hZ
[INFO] [stdout] [2m2026-03-27T19:02:57.033228Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [246.09254, 244.05829, 245.90633]
[INFO] [stdout] [2m2026-03-27T19:02:57.033270Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 15
[INFO] [stdout] [2m2026-03-27T19:02:57.033355Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 245.90633
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-03-27T19:02:57.034348Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 179.21141 at 44100hZ = 246.07808hZ
[INFO] [stdout] [2m2026-03-27T19:02:57.034421Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [246.09254, 246.07808, 245.90633]
[INFO] [stdout] [2m2026-03-27T19:02:57.034463Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 16
[INFO] [stdout] [2m2026-03-27T19:02:57.034552Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 246.07808
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-03-27T19:02:57.035029Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 58 with 183 (0.39160156 vs 0.8769531)
[INFO] [stdout] [2m2026-03-27T19:02:57.035110Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 183 with 895 (0.8769531 vs 0.93847656)
[INFO] [stdout] [2m2026-03-27T19:02:57.035752Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 895.3624 at 44100hZ = 49.2538hZ
[INFO] [stdout] [2m2026-03-27T19:02:57.035833Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Checking for harmonics & subharmonics
[INFO] [stdout] [2m2026-03-27T19:02:57.035904Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [246.09254, 246.07808, 246.269]
[INFO] [stdout] [2m2026-03-27T19:02:57.035993Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 17
[INFO] [stdout] [2m2026-03-27T19:02:57.036041Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 246.09254
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-03-27T19:02:57.042208Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 359 is a subharmonic of 177 (0.9404297 vs 0.9355469)
[INFO] [stdout] [2m2026-03-27T19:02:57.042581Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 181 is a subharmonic of 177 (0.94921875 vs 0.9404297)
[INFO] [stdout] [2m2026-03-27T19:02:57.043598Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 179.625 at 44100hZ = 245.51149hZ
[INFO] [stdout] [2m2026-03-27T19:02:57.043669Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [245.51149, 246.07808, 246.269]
[INFO] [stdout] [2m2026-03-27T19:02:57.043704Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 18
[INFO] [stdout] [2m2026-03-27T19:02:57.043751Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 246.07808
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-03-27T19:02:57.046574Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 53 with 177 (0.34375 vs 0.921875)
[INFO] [stdout] [2m2026-03-27T19:02:57.046673Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 360 is a subharmonic of 177 (0.9277344 vs 0.921875)
[INFO] [stdout] [2m2026-03-27T19:02:57.046707Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 897 is a subharmonic of 177 (0.9345703 vs 0.9277344)
[INFO] [stdout] [2m2026-03-27T19:02:57.046774Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 179 is a subharmonic of 177 (0.94140625 vs 0.9345703)
[INFO] [stdout] [2m2026-03-27T19:02:57.047367Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 179.15118 at 44100hZ = 246.16081hZ
[INFO] [stdout] [2m2026-03-27T19:02:57.047447Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [245.51149, 246.16081, 246.269]
[INFO] [stdout] [2m2026-03-27T19:02:57.047489Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 19
[INFO] [stdout] [2m2026-03-27T19:02:57.047565Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 246.16081
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-03-27T19:02:57.047886Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 362 is a subharmonic of 183 (0.9189453 vs 0.9160156)
[INFO] [stdout] [2m2026-03-27T19:02:57.048063Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 183 with 537 (0.9189453 vs 0.9501953)
[INFO] [stdout] [2m2026-03-27T19:02:57.049711Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 178.81647 at 44100hZ = 246.62158hZ
[INFO] [stdout] [2m2026-03-27T19:02:57.051732Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [245.51149, 246.16081, 246.62158]
[INFO] [stdout] [2m2026-03-27T19:02:57.051825Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 20
[INFO] [stdout] [2m2026-03-27T19:02:57.051864Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 246.16081
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-03-27T19:02:57.052885Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 46 with 175 (0.29882813 vs 0.8466797)
[INFO] [stdout] [2m2026-03-27T19:02:57.053707Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 175 with 358 (0.8466797 vs 0.92285156)
[INFO] [stdout] [2m2026-03-27T19:02:57.053774Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 716 is a subharmonic of 358 (0.9375 vs 0.92285156)
[INFO] [stdout] [2m2026-03-27T19:02:57.054888Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 358.0625 at 44100hZ = 123.16286hZ
[INFO] [stdout] [2m2026-03-27T19:02:57.055000Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Checking for harmonics & subharmonics
[INFO] [stdout] [2m2026-03-27T19:02:57.055042Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [246.32571, 246.16081, 246.62158]
[INFO] [stdout] [2m2026-03-27T19:02:57.055168Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 21
[INFO] [stdout] [2m2026-03-27T19:02:57.055305Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 246.32571
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-03-27T19:02:57.056036Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 46 with 171 (0.27539063 vs 0.8095703)
[INFO] [stdout] [2m2026-03-27T19:02:57.056177Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 171 with 353 (0.8095703 vs 0.84375)
[INFO] [stdout] [2m2026-03-27T19:02:57.056266Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 353 with 717 (0.84375 vs 0.92089844)
[INFO] [stdout] [2m2026-03-27T19:02:57.056995Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 359.67178 at 44100hZ = 122.611786hZ
[INFO] [stdout] [2m2026-03-27T19:02:57.057140Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Checking for harmonics & subharmonics
[INFO] [stdout] [2m2026-03-27T19:02:57.057258Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [246.32571, 245.22357, 246.62158]
[INFO] [stdout] [2m2026-03-27T19:02:57.057351Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 22
[INFO] [stdout] [2m2026-03-27T19:02:57.057482Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 246.32571
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-03-27T19:02:57.058342Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 100 with 636 (0.5751953 vs 0.6044922)
[INFO] [stdout] [2m2026-03-27T19:02:57.058414Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 715 is a subharmonic of 182 (0.93359375 vs 0.9326172)
[INFO] [stdout] [2m2026-03-27T19:02:57.058445Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 897 is a subharmonic of 182 (0.9511719 vs 0.93359375)
[INFO] [stdout] [2m2026-03-27T19:02:57.059142Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 179.24347 at 44100hZ = 246.03407hZ
[INFO] [stdout] [2m2026-03-27T19:02:57.059445Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [246.32571, 245.22357, 246.03407]
[INFO] [stdout] [2m2026-03-27T19:02:57.060096Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 23
[INFO] [stdout] [2m2026-03-27T19:02:57.060261Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 246.03407
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-03-27T19:02:57.061205Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 44 with 179 (0.19238281 vs 0.95214844)
[INFO] [stdout] [2m2026-03-27T19:02:57.062286Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 179.3195 at 44100hZ = 245.92975hZ
[INFO] [stdout] [2m2026-03-27T19:02:57.062455Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [245.92975, 245.22357, 246.03407]
[INFO] [stdout] [2m2026-03-27T19:02:57.062669Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 24
[INFO] [stdout] [2m2026-03-27T19:02:57.062735Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 245.92975
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-03-27T19:02:57.063420Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 897 is a subharmonic of 178 (0.94140625 vs 0.93847656)
[INFO] [stdout] [2m2026-03-27T19:02:57.063491Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 179 is a subharmonic of 178 (0.94140625 vs 0.94140625)
[INFO] [stdout] [2m2026-03-27T19:02:57.064077Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 179.0091 at 44100hZ = 246.3562hZ
[INFO] [stdout] [2m2026-03-27T19:02:57.064147Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [245.92975, 246.3562, 246.03407]
[INFO] [stdout] [2m2026-03-27T19:02:57.064190Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 25
[INFO] [stdout] [2m2026-03-27T19:02:57.064265Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 246.03407
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-03-27T19:02:57.064705Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 45 with 141 (0.17578125 vs 0.20507813)
[INFO] [stdout] [2m2026-03-27T19:02:57.064781Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 141 with 278 (0.20507813 vs 0.7314453)
[INFO] [stdout] [2m2026-03-27T19:02:57.064827Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 714 is a subharmonic of 357 (0.9453125 vs 0.94140625)
[INFO] [stdout] [2m2026-03-27T19:02:57.065480Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 357.0802 at 44100hZ = 123.50167hZ
[INFO] [stdout] [2m2026-03-27T19:02:57.065549Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Checking for harmonics & subharmonics
[INFO] [stdout] [2m2026-03-27T19:02:57.065583Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [245.92975, 246.3562, 247.00334]
[INFO] [stdout] [2m2026-03-27T19:02:57.065638Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 26
[INFO] [stdout] [2m2026-03-27T19:02:57.065673Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 246.3562
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-03-27T19:02:57.066135Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 32 with 210 (0.29296875 vs 0.33398438)
[INFO] [stdout] [2m2026-03-27T19:02:57.066222Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 705 is a subharmonic of 346 (0.7246094 vs 0.70703125)
[INFO] [stdout] [2m2026-03-27T19:02:57.066307Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 719 is a subharmonic of 178 (0.9267578 vs 0.9238281)
[INFO] [stdout] [2m2026-03-27T19:02:57.066369Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 180 is a subharmonic of 178 (0.9355469 vs 0.9267578)
[INFO] [stdout] [2m2026-03-27T19:02:57.066996Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 180.71922 at 44100hZ = 244.02495hZ
[INFO] [stdout] [2m2026-03-27T19:02:57.067066Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [244.02495, 246.3562, 247.00334]
[INFO] [stdout] [2m2026-03-27T19:02:57.067109Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 27
[INFO] [stdout] [2m2026-03-27T19:02:57.067184Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 246.3562
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-03-27T19:02:57.067856Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 39 with 82 (0.19921875 vs 0.7421875)
[INFO] [stdout] [2m2026-03-27T19:02:57.067938Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 268 is a subharmonic of 82 (0.75683594 vs 0.7421875)
[INFO] [stdout] [2m2026-03-27T19:02:57.068024Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 620 is a subharmonic of 82 (0.7685547 vs 0.75683594)
[INFO] [stdout] [2m2026-03-27T19:02:57.068068Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 801 is a subharmonic of 82 (0.79003906 vs 0.7685547)
[INFO] [stdout] [2m2026-03-27T19:02:57.068148Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 82 with 894 (0.79003906 vs 0.9082031)
[INFO] [stdout] [2m2026-03-27T19:02:57.069001Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 359.01334 at 44100hZ = 122.83666hZ
[INFO] [stdout] [2m2026-03-27T19:02:57.069071Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Checking for harmonics & subharmonics
[INFO] [stdout] [2m2026-03-27T19:02:57.069109Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [244.02495, 245.67332, 247.00334]
[INFO] [stdout] [2m2026-03-27T19:02:57.069194Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 28
[INFO] [stdout] [2m2026-03-27T19:02:57.069232Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 245.67332
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-03-27T19:02:57.069543Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 48 with 145 (0.14550781 vs 0.23339844)
[INFO] [stdout] [2m2026-03-27T19:02:57.069626Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 361 is a subharmonic of 183 (0.92578125 vs 0.91503906)
[INFO] [stdout] [2m2026-03-27T19:02:57.069690Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 539 is a subharmonic of 183 (0.9433594 vs 0.92578125)
[INFO] [stdout] [2m2026-03-27T19:02:57.069749Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 717 is a subharmonic of 183 (0.9482422 vs 0.9433594)
[INFO] [stdout] [2m2026-03-27T19:02:57.070584Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 178.93088 at 44100hZ = 246.46388hZ
[INFO] [stdout] [2m2026-03-27T19:02:57.070653Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [244.02495, 245.67332, 246.46388]
[INFO] [stdout] [2m2026-03-27T19:02:57.070690Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 29
[INFO] [stdout] [2m2026-03-27T19:02:57.070748Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 245.67332
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-03-27T19:02:57.073123Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 896.38196 at 44100hZ = 49.197777hZ
[INFO] [stdout] [2m2026-03-27T19:02:57.073210Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Checking for harmonics & subharmonics
[INFO] [stdout] [2m2026-03-27T19:02:57.073253Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [245.98889, 245.67332, 246.46388]
[INFO] [stdout] [2m2026-03-27T19:02:57.073336Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 30
[INFO] [stdout] [2m2026-03-27T19:02:57.073375Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 245.98889
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-03-27T19:02:57.073842Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 42 with 91 (0.125 vs 0.85546875)
[INFO] [stdout] [2m2026-03-27T19:02:57.073906Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 91 with 179 (0.85546875 vs 0.9316406)
[INFO] [stdout] [2m2026-03-27T19:02:57.073999Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 898 is a subharmonic of 179 (0.9394531 vs 0.9316406)
[INFO] [stdout] [2m2026-03-27T19:02:57.074983Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 179.85263 at 44100hZ = 245.20074hZ
[INFO] [stdout] [2m2026-03-27T19:02:57.075063Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [245.98889, 245.20074, 246.46388]
[INFO] [stdout] [2m2026-03-27T19:02:57.075105Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 31
[INFO] [stdout] [2m2026-03-27T19:02:57.075197Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 245.98889
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-03-27T19:02:57.075654Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 717 is a subharmonic of 182 (0.93847656 vs 0.9199219)
[INFO] [stdout] [2m2026-03-27T19:02:57.075757Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 359 is a subharmonic of 182 (0.93847656 vs 0.93847656)
[INFO] [stdout] [2m2026-03-27T19:02:57.075840Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 716 is a subharmonic of 182 (0.9394531 vs 0.93847656)
[INFO] [stdout] [2m2026-03-27T19:02:57.075998Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 358 is a subharmonic of 182 (0.94140625 vs 0.9394531)
[INFO] [stdout] [2m2026-03-27T19:02:57.076815Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 179.6923 at 44100hZ = 245.41953hZ
[INFO] [stdout] [2m2026-03-27T19:02:57.076888Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [245.98889, 245.20074, 245.41953]
[INFO] [stdout] [2m2026-03-27T19:02:57.076941Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 32
[INFO] [stdout] [2m2026-03-27T19:02:57.077031Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 245.41953
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-03-27T19:02:57.077341Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 98 with 183 (0.81152344 vs 0.89941406)
[INFO] [stdout] [2m2026-03-27T19:02:57.077409Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 183 with 716 (0.89941406 vs 0.92285156)
[INFO] [stdout] [2m2026-03-27T19:02:57.078019Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 895.5994 at 44100hZ = 49.240765hZ
[INFO] [stdout] [2m2026-03-27T19:02:57.078087Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Checking for harmonics & subharmonics
[INFO] [stdout] [2m2026-03-27T19:02:57.078126Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [246.20383, 245.20074, 245.41953]
[INFO] [stdout] [2m2026-03-27T19:02:57.078214Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 33
[INFO] [stdout] [2m2026-03-27T19:02:57.078253Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 245.41953
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-03-27T19:02:57.078726Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 537 is a subharmonic of 181 (0.9199219 vs 0.9160156)
[INFO] [stdout] [2m2026-03-27T19:02:57.078794Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 895 is a subharmonic of 181 (0.921875 vs 0.9199219)
[INFO] [stdout] [2m2026-03-27T19:02:57.079701Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 179.46667 at 44100hZ = 245.72807hZ
[INFO] [stdout] [2m2026-03-27T19:02:57.079774Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [246.20383, 245.72807, 245.41953]
[INFO] [stdout] [2m2026-03-27T19:02:57.079817Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 34
[INFO] [stdout] [2m2026-03-27T19:02:57.079894Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 245.72807
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-03-27T19:02:57.080353Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 46 with 184 (0.1875 vs 0.8095703)
[INFO] [stdout] [2m2026-03-27T19:02:57.080418Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 536 is a subharmonic of 184 (0.81152344 vs 0.8095703)
[INFO] [stdout] [2m2026-03-27T19:02:57.080497Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 723 is a subharmonic of 179 (0.8408203 vs 0.83984375)
[INFO] [stdout] [2m2026-03-27T19:02:57.080561Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 898 is a subharmonic of 179 (0.8457031 vs 0.8408203)
[INFO] [stdout] [2m2026-03-27T19:02:57.080606Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 713 is a subharmonic of 179 (0.86621094 vs 0.8457031)
[INFO] [stdout] [2m2026-03-27T19:02:57.081323Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 178.55682 at 44100hZ = 246.9802hZ
[INFO] [stdout] [2m2026-03-27T19:02:57.081389Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [246.20383, 245.72807, 246.9802]
[INFO] [stdout] [2m2026-03-27T19:02:57.081423Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 35
[INFO] [stdout] [2m2026-03-27T19:02:57.081476Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 246.20383
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-03-27T19:02:57.081924Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 40 with 92 (0.19433594 vs 0.8388672)
[INFO] [stdout] [2m2026-03-27T19:02:57.082227Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 173 is a subharmonic of 92 (0.85253906 vs 0.8388672)
[INFO] [stdout] [2m2026-03-27T19:02:57.082437Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 92 with 537 (0.85253906 vs 0.88964844)
[INFO] [stdout] [2m2026-03-27T19:02:57.083225Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 897 is a subharmonic of 179 (0.91796875 vs 0.9169922)
[INFO] [stdout] [2m2026-03-27T19:02:57.084357Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 178.69363 at 44100hZ = 246.7911hZ
[INFO] [stdout] [2m2026-03-27T19:02:57.084436Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [246.7911, 245.72807, 246.9802]
[INFO] [stdout] [2m2026-03-27T19:02:57.084569Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 36
[INFO] [stdout] [2m2026-03-27T19:02:57.084752Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 246.7911
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-03-27T19:02:57.085416Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 98 with 182 (0.7910156 vs 0.890625)
[INFO] [stdout] [2m2026-03-27T19:02:57.085583Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 541 is a subharmonic of 182 (0.89746094 vs 0.890625)
[INFO] [stdout] [2m2026-03-27T19:02:57.085656Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 894 is a subharmonic of 177 (0.9033203 vs 0.9033203)
[INFO] [stdout] [2m2026-03-27T19:02:57.085726Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 356 is a subharmonic of 177 (0.9169922 vs 0.9033203)
[INFO] [stdout] [2m2026-03-27T19:02:57.085783Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 897 is a subharmonic of 177 (0.9277344 vs 0.9169922)
[INFO] [stdout] [2m2026-03-27T19:02:57.086562Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 179.63394 at 44100hZ = 245.49927hZ
[INFO] [stdout] [2m2026-03-27T19:02:57.086633Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [246.7911, 245.49927, 246.9802]
[INFO] [stdout] [2m2026-03-27T19:02:57.086747Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 37
[INFO] [stdout] [2m2026-03-27T19:02:57.086806Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 246.7911
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-03-27T19:02:57.087152Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 47 with 126 (0.14648438 vs 0.20898438)
[INFO] [stdout] [2m2026-03-27T19:02:57.087226Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 720 is a subharmonic of 182 (0.8847656 vs 0.8808594)
[INFO] [stdout] [2m2026-03-27T19:02:57.087308Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 357 is a subharmonic of 182 (0.89453125 vs 0.8847656)
[INFO] [stdout] [2m2026-03-27T19:02:57.087365Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 717 is a subharmonic of 182 (0.89941406 vs 0.89453125)
[INFO] [stdout] [2m2026-03-27T19:02:57.087854Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 179.28572 at 44100hZ = 245.97609hZ
[INFO] [stdout] [2m2026-03-27T19:02:57.087989Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [246.7911, 245.49927, 245.97609]
[INFO] [stdout] [2m2026-03-27T19:02:57.088051Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 38
[INFO] [stdout] [2m2026-03-27T19:02:57.088090Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 245.97609
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-03-27T19:02:57.088555Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 354 is a subharmonic of 180 (0.86035156 vs 0.85546875)
[INFO] [stdout] [2m2026-03-27T19:02:57.088627Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 539 is a subharmonic of 180 (0.86816406 vs 0.86035156)
[INFO] [stdout] [2m2026-03-27T19:02:57.088671Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 902 is a subharmonic of 180 (0.8769531 vs 0.86816406)
[INFO] [stdout] [2m2026-03-27T19:02:57.088773Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 180 with 359 (0.8769531 vs 0.90722656)
[INFO] [stdout] [2m2026-03-27T19:02:57.089461Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 360.53333 at 44100hZ = 122.31879hZ
[INFO] [stdout] [2m2026-03-27T19:02:57.089544Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Checking for harmonics & subharmonics
[INFO] [stdout] [2m2026-03-27T19:02:57.089584Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [244.63757, 245.49927, 245.97609]
[INFO] [stdout] [2m2026-03-27T19:02:57.089677Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 39
[INFO] [stdout] [2m2026-03-27T19:02:57.089724Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 245.49927
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-03-27T19:02:57.090229Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 187 with 365 (0.8144531 vs 0.8544922)
[INFO] [stdout] [2m2026-03-27T19:02:57.090401Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 178 with 359 (0.88964844 vs 0.91308594)
[INFO] [stdout] [2m2026-03-27T19:02:57.090898Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 895.1538 at 44100hZ = 49.265278hZ
[INFO] [stdout] [2m2026-03-27T19:02:57.090995Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Checking for harmonics & subharmonics
[INFO] [stdout] [2m2026-03-27T19:02:57.091035Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [244.63757, 246.32639, 245.97609]
[INFO] [stdout] [2m2026-03-27T19:02:57.091125Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 40
[INFO] [stdout] [2m2026-03-27T19:02:57.091164Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 245.97609
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-03-27T19:02:57.091649Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 705 is a subharmonic of 76 (0.70410156 vs 0.6953125)
[INFO] [stdout] [2m2026-03-27T19:02:57.091722Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 76 with 445 (0.70410156 vs 0.8496094)
[INFO] [stdout] [2m2026-03-27T19:02:57.092333Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 717.7778 at 44100hZ = 61.43963hZ
[INFO] [stdout] [2m2026-03-27T19:02:57.092413Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Checking for harmonics & subharmonics
[INFO] [stdout] [2m2026-03-27T19:02:57.092452Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [244.63757, 246.32639, 245.75851]
[INFO] [stdout] [2m2026-03-27T19:02:57.092539Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 41
[INFO] [stdout] [2m2026-03-27T19:02:57.092580Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 245.75851
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-03-27T19:02:57.092889Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 262 is a subharmonic of 81 (0.8105469 vs 0.8046875)
[INFO] [stdout] [2m2026-03-27T19:02:57.093010Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 718 is a subharmonic of 81 (0.8300781 vs 0.8105469)
[INFO] [stdout] [2m2026-03-27T19:02:57.093092Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 358 is a subharmonic of 181 (0.8925781 vs 0.88671875)
[INFO] [stdout] [2m2026-03-27T19:02:57.093682Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 180.30833 at 44100hZ = 244.58104hZ
[INFO] [stdout] [2m2026-03-27T19:02:57.093753Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [244.58104, 246.32639, 245.75851]
[INFO] [stdout] [2m2026-03-27T19:02:57.093793Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 42
[INFO] [stdout] [2m2026-03-27T19:02:57.093873Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 245.75851
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-03-27T19:02:57.094344Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 52 with 354 (0.25683594 vs 0.8232422)
[INFO] [stdout] [2m2026-03-27T19:02:57.095166Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 356.06668 at 44100hZ = 123.8532hZ
[INFO] [stdout] [2m2026-03-27T19:02:57.095244Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Checking for harmonics & subharmonics
[INFO] [stdout] [2m2026-03-27T19:02:57.095280Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [244.58104, 247.7064, 245.75851]
[INFO] [stdout] [2m2026-03-27T19:02:57.095342Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 43
[INFO] [stdout] [2m2026-03-27T19:02:57.095377Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 245.75851
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-03-27T19:02:57.095851Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 173 with 895 (0.81152344 vs 0.85546875)
[INFO] [stdout] [2m2026-03-27T19:02:57.096403Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 893.1944 at 44100hZ = 49.373352hZ
[INFO] [stdout] [2m2026-03-27T19:02:57.096475Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Checking for harmonics & subharmonics
[INFO] [stdout] [2m2026-03-27T19:02:57.096516Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [244.58104, 247.7064, 246.86676]
[INFO] [stdout] [2m2026-03-27T19:02:57.096596Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 44
[INFO] [stdout] [2m2026-03-27T19:02:57.096636Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 246.86676
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-03-27T19:02:57.097155Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 91 with 538 (0.7529297 vs 0.8222656)
[INFO] [stdout] [2m2026-03-27T19:02:57.097838Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 544.89087 at 44100hZ = 80.93364hZ
[INFO] [stdout] [2m2026-03-27T19:02:57.097906Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Checking for harmonics & subharmonics
[INFO] [stdout] [2m2026-03-27T19:02:57.097986Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [242.80092, 247.7064, 246.86676]
[INFO] [stdout] [2m2026-03-27T19:02:57.098045Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 45
[INFO] [stdout] [2m2026-03-27T19:02:57.098083Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 246.86676
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-03-27T19:02:57.098548Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 91 with 898 (0.7861328 vs 0.8574219)
[INFO] [stdout] [2m2026-03-27T19:02:57.099154Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 896.50793 at 44100hZ = 49.190865hZ
[INFO] [stdout] [2m2026-03-27T19:02:57.099227Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Checking for harmonics & subharmonics
[INFO] [stdout] [2m2026-03-27T19:02:57.099267Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [242.80092, 245.95432, 246.86676]
[INFO] [stdout] [2m2026-03-27T19:02:57.099346Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 46
[INFO] [stdout] [2m2026-03-27T19:02:57.099386Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 245.95432
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-03-27T19:02:57.100269Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 81.94286 at 44100hZ = 538.1799hZ
[INFO] [stdout] [2m2026-03-27T19:02:57.100405Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Not long enough since shift to check for harmonics (0)
[INFO] [stdout] [2m2026-03-27T19:02:57.100454Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Failed to find frequency
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-03-27T19:02:57.100872Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 136 with 539 (0.4560547 vs 0.57128906)
[INFO] [stdout] [2m2026-03-27T19:02:57.100984Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 97 with 719 (0.6591797 vs 0.7158203)
[INFO] [stdout] [2m2026-03-27T19:02:57.101512Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 894.1667 at 44100hZ = 49.319664hZ
[INFO] [stdout] [2m2026-03-27T19:02:57.101583Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Not long enough since shift to check for harmonics (0)
[INFO] [stdout] [2m2026-03-27T19:02:57.101620Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Failed to find frequency
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-03-27T19:02:57.102109Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 358 with 711 (0.6484375 vs 0.6816406)
[INFO] [stdout] [2m2026-03-27T19:02:57.102868Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 89.9 at 44100hZ = 490.54504hZ
[INFO] [stdout] [2m2026-03-27T19:02:57.102991Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Not long enough since shift to check for harmonics (0)
[INFO] [stdout] [2m2026-03-27T19:02:57.103047Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Failed to find frequency
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-03-27T19:02:57.103497Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 88 with 178 (0.7011719 vs 0.74121094)
[INFO] [stdout] [2m2026-03-27T19:02:57.104464Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 175.37143 at 44100hZ = 251.46628hZ
[INFO] [stdout] [2m2026-03-27T19:02:57.104532Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [242.80092, 245.95432, 251.46628]
[INFO] [stdout] [2m2026-03-27T19:02:57.104572Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 0
[INFO] [stdout] [2m2026-03-27T19:02:57.104644Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 245.95432
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-03-27T19:02:57.105855Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 367.80002 at 44100hZ = 119.902115hZ
[INFO] [stdout] [2m2026-03-27T19:02:57.105942Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Not long enough since shift to check for harmonics (0)
[INFO] [stdout] [2m2026-03-27T19:02:57.106033Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Failed to find frequency
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-03-27T19:02:57.106482Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 93 with 535 (0.51953125 vs 0.5966797)
[INFO] [stdout] [2m2026-03-27T19:02:57.107425Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 172.85713 at 44100hZ = 255.12398hZ
[INFO] [stdout] [2m2026-03-27T19:02:57.107493Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Not long enough since shift to check for harmonics (0)
[INFO] [stdout] [2m2026-03-27T19:02:57.107531Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Failed to find frequency
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-03-27T19:02:57.108008Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 147 with 451 (0.35351563 vs 0.47558594)
[INFO] [stdout] [2m2026-03-27T19:02:57.108738Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 736.7778 at 44100hZ = 59.855225hZ
[INFO] [stdout] [2m2026-03-27T19:02:57.108807Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Not long enough since shift to check for harmonics (0)
[INFO] [stdout] [2m2026-03-27T19:02:57.108858Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Failed to find frequency
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-03-27T19:02:57.109912Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 437.5 at 44100hZ = 100.8hZ
[INFO] [stdout] [2m2026-03-27T19:02:57.110004Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Not long enough since shift to check for harmonics (0)
[INFO] [stdout] [2m2026-03-27T19:02:57.110050Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Unconfident shift at 0.8388672
[INFO] [stdout] [2m2026-03-27T19:02:57.110122Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Failed to find frequency
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-03-27T19:02:57.111825Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 198.36363 at 44100hZ = 222.31898hZ
[INFO] [stdout] [2m2026-03-27T19:02:57.111897Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Not long enough since shift to check for harmonics (0)
[INFO] [stdout] [2m2026-03-27T19:02:57.111985Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Failed to find frequency
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-03-27T19:02:57.113539Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 348.4 at 44100hZ = 126.57864hZ
[INFO] [stdout] [2m2026-03-27T19:02:57.113623Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Not long enough since shift to check for harmonics (0)
[INFO] [stdout] [2m2026-03-27T19:02:57.113663Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Failed to find frequency
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-03-27T19:02:57.114898Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 31 at 44100hZ = 1422.5807hZ
[INFO] [stdout] [2m2026-03-27T19:02:57.115000Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Not long enough since shift to check for harmonics (0)
[INFO] [stdout] [2m2026-03-27T19:02:57.115040Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Unconfident shift at 0.80078125
[INFO] [stdout] [2m2026-03-27T19:02:57.115133Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Failed to find frequency
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-03-27T19:02:57.117051Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 16.5 at 44100hZ = 2672.7273hZ
[INFO] [stdout] [2m2026-03-27T19:02:57.117139Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Not long enough since shift to check for harmonics (0)
[INFO] [stdout] [2m2026-03-27T19:02:57.117183Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Unconfident shift at 0.8125
[INFO] [stdout] [2m2026-03-27T19:02:57.117264Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Failed to find frequency
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-03-27T19:02:57.118878Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 31 at 44100hZ = 1422.5807hZ
[INFO] [stdout] [2m2026-03-27T19:02:57.118990Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Not long enough since shift to check for harmonics (0)
[INFO] [stdout] [2m2026-03-27T19:02:57.119030Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Confident shift at 0.90625
[INFO] [stdout] [2m2026-03-27T19:02:57.119079Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [1422.5807, 245.95432, 251.46628]
[INFO] [stdout] [2m2026-03-27T19:02:57.119149Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 0
[INFO] [stdout] [2m2026-03-27T19:02:57.119189Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 251.46628
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-03-27T19:02:57.119726Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 871.0833 at 44100hZ = 50.626617hZ
[INFO] [stdout] [2m2026-03-27T19:02:57.119802Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Not long enough since shift to check for harmonics (0)
[INFO] [stdout] [2m2026-03-27T19:02:57.119841Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Failed to find frequency
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-03-27T19:02:57.120705Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 31 at 44100hZ = 1422.5807hZ
[INFO] [stdout] [2m2026-03-27T19:02:57.120785Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Not long enough since shift to check for harmonics (0)
[INFO] [stdout] [2m2026-03-27T19:02:57.120824Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Failed to find frequency
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-03-27T19:02:57.122359Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 31 at 44100hZ = 1422.5807hZ
[INFO] [stdout] [2m2026-03-27T19:02:57.122441Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Not long enough since shift to check for harmonics (0)
[INFO] [stdout] [2m2026-03-27T19:02:57.122481Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Confident shift at 0.9375
[INFO] [stdout] [2m2026-03-27T19:02:57.122569Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [1422.5807, 1422.5807, 251.46628]
[INFO] [stdout] [2m2026-03-27T19:02:57.122650Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift detected, reset frames from 0
[INFO] [stdout] [2m2026-03-27T19:02:57.122712Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 1422.5807
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-03-27T19:02:57.124591Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 31 at 44100hZ = 1422.5807hZ
[INFO] [stdout] [2m2026-03-27T19:02:57.124667Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [1422.5807, 1422.5807, 1422.5807]
[INFO] [stdout] [2m2026-03-27T19:02:57.124704Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 0
[INFO] [stdout] [2m2026-03-27T19:02:57.124784Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 1422.5807
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-03-27T19:02:57.125649Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 31 at 44100hZ = 1422.5807hZ
[INFO] [stdout] [2m2026-03-27T19:02:57.125725Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [1422.5807, 1422.5807, 1422.5807]
[INFO] [stdout] [2m2026-03-27T19:02:57.125762Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 1
[INFO] [stdout] [2m2026-03-27T19:02:57.125830Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 1422.5807
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-03-27T19:02:57.127798Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 33.11111 at 44100hZ = 1331.8793hZ
[INFO] [stdout] [2m2026-03-27T19:02:57.127880Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Not long enough since shift to check for harmonics (2)
[INFO] [stdout] [2m2026-03-27T19:02:57.127928Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Confident shift at 0.9375
[INFO] [stdout] [2m2026-03-27T19:02:57.128026Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [1422.5807, 1331.8793, 1422.5807]
[INFO] [stdout] [2m2026-03-27T19:02:57.128069Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 2
[INFO] [stdout] [2m2026-03-27T19:02:57.128154Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 1422.5807
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-03-27T19:02:57.130558Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 33.11111 at 44100hZ = 1331.8793hZ
[INFO] [stdout] [2m2026-03-27T19:02:57.130639Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Not long enough since shift to check for harmonics (3)
[INFO] [stdout] [2m2026-03-27T19:02:57.130674Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Confident shift at 0.9375
[INFO] [stdout] [2m2026-03-27T19:02:57.130733Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [1422.5807, 1331.8793, 1331.8793]
[INFO] [stdout] [2m2026-03-27T19:02:57.130773Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift detected, reset frames from 3
[INFO] [stdout] [2m2026-03-27T19:02:57.130830Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 1331.8793
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-03-27T19:02:57.133285Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 33.11111 at 44100hZ = 1331.8793hZ
[INFO] [stdout] [2m2026-03-27T19:02:57.133373Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [1331.8793, 1331.8793, 1331.8793]
[INFO] [stdout] [2m2026-03-27T19:02:57.133418Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 0
[INFO] [stdout] [2m2026-03-27T19:02:57.133498Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 1331.8793
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-03-27T19:02:57.135901Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 33.11111 at 44100hZ = 1331.8793hZ
[INFO] [stdout] [2m2026-03-27T19:02:57.136017Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [1331.8793, 1331.8793, 1331.8793]
[INFO] [stdout] [2m2026-03-27T19:02:57.136062Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 1
[INFO] [stdout] [2m2026-03-27T19:02:57.136143Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 1331.8793
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-03-27T19:02:57.138545Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 153 at 44100hZ = 288.2353hZ
[INFO] [stdout] [2m2026-03-27T19:02:57.138629Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Not long enough since shift to check for harmonics (2)
[INFO] [stdout] [2m2026-03-27T19:02:57.138672Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Confident shift at 1
[INFO] [stdout] [2m2026-03-27T19:02:57.138752Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [1331.8793, 1331.8793, 288.2353]
[INFO] [stdout] [2m2026-03-27T19:02:57.138803Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 2
[INFO] [stdout] [2m2026-03-27T19:02:57.138888Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 1331.8793
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-03-27T19:02:57.139329Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Failed to find frequency
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-03-27T19:02:57.139790Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Failed to find frequency
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-03-27T19:02:57.140271Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 844 is a subharmonic of 173 (0.8310547 vs 0.8310547)
[INFO] [stdout] [2m2026-03-27T19:02:57.142288Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 33.11111 at 44100hZ = 1331.8793hZ
[INFO] [stdout] [2m2026-03-27T19:02:57.142367Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [1331.8793, 1331.8793, 288.2353]
[INFO] [stdout] [2m2026-03-27T19:02:57.142411Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 0
[INFO] [stdout] [2m2026-03-27T19:02:57.142490Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 1331.8793
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-03-27T19:02:57.142939Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Failed to find frequency
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-03-27T19:02:57.145179Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 33.11111 at 44100hZ = 1331.8793hZ
[INFO] [stdout] [2m2026-03-27T19:02:57.145266Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [1331.8793, 1331.8793, 288.2353]
[INFO] [stdout] [2m2026-03-27T19:02:57.145308Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 0
[INFO] [stdout] [2m2026-03-27T19:02:57.145387Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 1331.8793
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-03-27T19:02:57.147260Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 926 at 44100hZ = 47.62419hZ
[INFO] [stdout] [2m2026-03-27T19:02:57.147344Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Not long enough since shift to check for harmonics (1)
[INFO] [stdout] [2m2026-03-27T19:02:57.147382Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Confident shift at 0.9707031
[INFO] [stdout] [2m2026-03-27T19:02:57.147461Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [1331.8793, 1331.8793, 47.62419]
[INFO] [stdout] [2m2026-03-27T19:02:57.147508Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 1
[INFO] [stdout] [2m2026-03-27T19:02:57.147583Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 1331.8793
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-03-27T19:02:57.150066Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 33.11111 at 44100hZ = 1331.8793hZ
[INFO] [stdout] [2m2026-03-27T19:02:57.150153Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [1331.8793, 1331.8793, 47.62419]
[INFO] [stdout] [2m2026-03-27T19:02:57.150198Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 2
[INFO] [stdout] [2m2026-03-27T19:02:57.150271Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 1331.8793
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-03-27T19:02:57.150867Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m False correlation check...
[INFO] [stdout] [2m2026-03-27T19:02:57.150938Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Failed to find frequency
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-03-27T19:02:57.151442Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 87.9 at 44100hZ = 501.70648hZ
[INFO] [stdout] [2m2026-03-27T19:02:57.151528Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Not long enough since shift to check for harmonics (0)
[INFO] [stdout] [2m2026-03-27T19:02:57.151567Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Failed to find frequency
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-03-27T19:02:57.152263Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 87.9 at 44100hZ = 501.70648hZ
[INFO] [stdout] [2m2026-03-27T19:02:57.152327Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Not long enough since shift to check for harmonics (0)
[INFO] [stdout] [2m2026-03-27T19:02:57.152369Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Failed to find frequency
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-03-27T19:02:57.152837Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Failed to find frequency
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-03-27T19:02:57.155125Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 38.375 at 44100hZ = 1149.1857hZ
[INFO] [stdout] [2m2026-03-27T19:02:57.155188Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Not long enough since shift to check for harmonics (0)
[INFO] [stdout] [2m2026-03-27T19:02:57.155216Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Confident shift at 0.9375
[INFO] [stdout] [2m2026-03-27T19:02:57.155241Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [1331.8793, 1149.1857, 47.62419]
[INFO] [stdout] [2m2026-03-27T19:02:57.155301Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift detected, reset frames from 0
[INFO] [stdout] [2m2026-03-27T19:02:57.155327Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 1149.1857
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-03-27T19:02:57.157489Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 38.375 at 44100hZ = 1149.1857hZ
[INFO] [stdout] [2m2026-03-27T19:02:57.157565Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [1331.8793, 1149.1857, 1149.1857]
[INFO] [stdout] [2m2026-03-27T19:02:57.157695Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 0
[INFO] [stdout] [2m2026-03-27T19:02:57.157754Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 1149.1857
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-03-27T19:02:57.160128Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 174.66667 at 44100hZ = 252.48091hZ
[INFO] [stdout] [2m2026-03-27T19:02:57.160220Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Not long enough since shift to check for harmonics (1)
[INFO] [stdout] [2m2026-03-27T19:02:57.160261Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Confident shift at 1
[INFO] [stdout] [2m2026-03-27T19:02:57.160347Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [252.48091, 1149.1857, 1149.1857]
[INFO] [stdout] [2m2026-03-27T19:02:57.160384Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 1
[INFO] [stdout] [2m2026-03-27T19:02:57.160455Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 1149.1857
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-03-27T19:02:57.160883Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Failed to find frequency
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-03-27T19:02:57.161357Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Failed to find frequency
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] test tests::test_from_file ... ok
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout] 
[INFO] [stdout] ---- tests::test_from_files stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'tests::test_from_files' (18) panicked at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tracing-subscriber-0.3.22/src/fmt/mod.rs:520:14:
[INFO] [stdout] Unable to install global subscriber: SetGlobalDefaultError("a global default trace dispatcher has already been set")
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5d5c079a89ea - std[f92b4c606f291077]::backtrace_rs::backtrace::libunwind::trace
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x5d5c079a89ea - std[f92b4c606f291077]::backtrace_rs::backtrace::trace_unsynchronized::<std[f92b4c606f291077]::sys::backtrace::_print_fmt::{closure#1}>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x5d5c079a89ea - std[f92b4c606f291077]::sys::backtrace::_print_fmt
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x5d5c079a89ea - <<std[f92b4c606f291077]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[786f478f706679df]::fmt::Display>::fmt
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x5d5c079be3ea - <core[786f478f706679df]::fmt::rt::Argument>::fmt
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x5d5c079be3ea - core[786f478f706679df]::fmt::write
[INFO] [stdout]    6:     0x5d5c079ad6e2 - std[f92b4c606f291077]::io::default_write_fmt::<alloc[64763625b5a07cdb]::vec::Vec<u8>>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/io/mod.rs:639:11
[INFO] [stdout]    7:     0x5d5c079ad6e2 - <alloc[64763625b5a07cdb]::vec::Vec<u8> as std[f92b4c606f291077]::io::Write>::write_fmt
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/io/mod.rs:1994:13
[INFO] [stdout]    8:     0x5d5c079870df - <std[f92b4c606f291077]::sys::backtrace::BacktraceLock>::print
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x5d5c079870df - std[f92b4c606f291077]::panicking::default_hook::{closure#0}
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panicking.rs:292:27
[INFO] [stdout]   10:     0x5d5c079a0b79 - std[f92b4c606f291077]::panicking::default_hook
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panicking.rs:316:9
[INFO] [stdout]   11:     0x5d5c07808c2c - <alloc[64763625b5a07cdb]::boxed::Box<dyn for<'a, 'b> core[786f478f706679df]::ops::function::Fn<(&'a std[f92b4c606f291077]::panic::PanicHookInfo<'b>,), Output = ()> + core[786f478f706679df]::marker::Sync + core[786f478f706679df]::marker::Send> as core[786f478f706679df]::ops::function::Fn<(&std[f92b4c606f291077]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/alloc/src/boxed.rs:2254:9
[INFO] [stdout]   12:     0x5d5c07808c2c - test[20e1f0ae6cad7a17]::test_main_with_exit_callback::<test[20e1f0ae6cad7a17]::test_main::{closure#0}>::{closure#0}
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/test/src/lib.rs:145:21
[INFO] [stdout]   13:     0x5d5c079a0df2 - <alloc[64763625b5a07cdb]::boxed::Box<dyn for<'a, 'b> core[786f478f706679df]::ops::function::Fn<(&'a std[f92b4c606f291077]::panic::PanicHookInfo<'b>,), Output = ()> + core[786f478f706679df]::marker::Sync + core[786f478f706679df]::marker::Send> as core[786f478f706679df]::ops::function::Fn<(&std[f92b4c606f291077]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/alloc/src/boxed.rs:2254:9
[INFO] [stdout]   14:     0x5d5c079a0df2 - std[f92b4c606f291077]::panicking::panic_with_hook
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panicking.rs:833:13
[INFO] [stdout]   15:     0x5d5c07987198 - std[f92b4c606f291077]::panicking::panic_handler::{closure#0}
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panicking.rs:698:13
[INFO] [stdout]   16:     0x5d5c0797ea79 - std[f92b4c606f291077]::sys::backtrace::__rust_end_short_backtrace::<std[f92b4c606f291077]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x5d5c07987ead - __rustc[8241495c18a89d70]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panicking.rs:689:5
[INFO] [stdout]   18:     0x5d5c079bebac - core[786f478f706679df]::panicking::panic_fmt
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x5d5c079be922 - core[786f478f706679df]::result::unwrap_failed
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/core/src/result.rs:1867:5
[INFO] [stdout]   20:     0x5d5c077e758b - <core[786f478f706679df]::result::Result<(), alloc[64763625b5a07cdb]::boxed::Box<dyn core[786f478f706679df]::error::Error + core[786f478f706679df]::marker::Sync + core[786f478f706679df]::marker::Send>>>::expect
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/core/src/result.rs:1185:23
[INFO] [stdout]   21:     0x5d5c0778bc60 - <tracing_subscriber[9d8cd18c8cf19199]::fmt::SubscriberBuilder>::init
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tracing-subscriber-0.3.22/src/fmt/mod.rs:520:14
[INFO] [stdout]   22:     0x5d5c0778d9c6 - bitstream_autocorrelation[e90cdf0f6dfdf548]::tests::test_from_files
[INFO] [stdout]                                at /opt/rustwide/workdir/src/lib.rs:137:14
[INFO] [stdout]   23:     0x5d5c07789417 - bitstream_autocorrelation[e90cdf0f6dfdf548]::tests::test_from_files::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/src/lib.rs:132:25
[INFO] [stdout]   24:     0x5d5c07756096 - <bitstream_autocorrelation[e90cdf0f6dfdf548]::tests::test_from_files::{closure#0} as core[786f478f706679df]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   25:     0x5d5c077fcd0b - <fn() -> core[786f478f706679df]::result::Result<(), alloc[64763625b5a07cdb]::string::String> as core[786f478f706679df]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   26:     0x5d5c077fcd0b - test[20e1f0ae6cad7a17]::__rust_begin_short_backtrace::<core[786f478f706679df]::result::Result<(), alloc[64763625b5a07cdb]::string::String>, fn() -> core[786f478f706679df]::result::Result<(), alloc[64763625b5a07cdb]::string::String>>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/test/src/lib.rs:663:18
[INFO] [stdout]   27:     0x5d5c078096fb - test[20e1f0ae6cad7a17]::run_test_in_process::{closure#0}
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/test/src/lib.rs:686:74
[INFO] [stdout]   28:     0x5d5c078096fb - <core[786f478f706679df]::panic::unwind_safe::AssertUnwindSafe<test[20e1f0ae6cad7a17]::run_test_in_process::{closure#0}> as core[786f478f706679df]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   29:     0x5d5c078096fb - std[f92b4c606f291077]::panicking::catch_unwind::do_call::<core[786f478f706679df]::panic::unwind_safe::AssertUnwindSafe<test[20e1f0ae6cad7a17]::run_test_in_process::{closure#0}>, core[786f478f706679df]::result::Result<(), alloc[64763625b5a07cdb]::string::String>>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panicking.rs:581:40
[INFO] [stdout]   30:     0x5d5c078096fb - std[f92b4c606f291077]::panicking::catch_unwind::<core[786f478f706679df]::result::Result<(), alloc[64763625b5a07cdb]::string::String>, core[786f478f706679df]::panic::unwind_safe::AssertUnwindSafe<test[20e1f0ae6cad7a17]::run_test_in_process::{closure#0}>>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panicking.rs:544:19
[INFO] [stdout]   31:     0x5d5c078096fb - std[f92b4c606f291077]::panic::catch_unwind::<core[786f478f706679df]::panic::unwind_safe::AssertUnwindSafe<test[20e1f0ae6cad7a17]::run_test_in_process::{closure#0}>, core[786f478f706679df]::result::Result<(), alloc[64763625b5a07cdb]::string::String>>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panic.rs:359:14
[INFO] [stdout]   32:     0x5d5c078096fb - test[20e1f0ae6cad7a17]::run_test_in_process
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/test/src/lib.rs:686:27
[INFO] [stdout]   33:     0x5d5c078096fb - test[20e1f0ae6cad7a17]::run_test::{closure#0}
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/test/src/lib.rs:607:43
[INFO] [stdout]   34:     0x5d5c07804e14 - test[20e1f0ae6cad7a17]::run_test::{closure#1}
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/test/src/lib.rs:637:41
[INFO] [stdout]   35:     0x5d5c07804e14 - std[f92b4c606f291077]::sys::backtrace::__rust_begin_short_backtrace::<test[20e1f0ae6cad7a17]::run_test::{closure#1}, ()>
[INFO] [stderr] error: test failed, to rerun pass `--lib`
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   36:     0x5d5c0780c302 - std[f92b4c606f291077]::thread::lifecycle::spawn_unchecked::<test[20e1f0ae6cad7a17]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/thread/lifecycle.rs:91:13
[INFO] [stdout]   37:     0x5d5c0780c302 - <core[786f478f706679df]::panic::unwind_safe::AssertUnwindSafe<std[f92b4c606f291077]::thread::lifecycle::spawn_unchecked<test[20e1f0ae6cad7a17]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}> as core[786f478f706679df]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   38:     0x5d5c0780c302 - std[f92b4c606f291077]::panicking::catch_unwind::do_call::<core[786f478f706679df]::panic::unwind_safe::AssertUnwindSafe<std[f92b4c606f291077]::thread::lifecycle::spawn_unchecked<test[20e1f0ae6cad7a17]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panicking.rs:581:40
[INFO] [stdout]   39:     0x5d5c0780c302 - std[f92b4c606f291077]::panicking::catch_unwind::<(), core[786f478f706679df]::panic::unwind_safe::AssertUnwindSafe<std[f92b4c606f291077]::thread::lifecycle::spawn_unchecked<test[20e1f0ae6cad7a17]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panicking.rs:544:19
[INFO] [stdout]   40:     0x5d5c0780c302 - std[f92b4c606f291077]::panic::catch_unwind::<core[786f478f706679df]::panic::unwind_safe::AssertUnwindSafe<std[f92b4c606f291077]::thread::lifecycle::spawn_unchecked<test[20e1f0ae6cad7a17]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panic.rs:359:14
[INFO] [stdout]   41:     0x5d5c0780c302 - std[f92b4c606f291077]::thread::lifecycle::spawn_unchecked::<test[20e1f0ae6cad7a17]::run_test::{closure#1}, ()>::{closure#1}
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/thread/lifecycle.rs:89:26
[INFO] [stdout]   42:     0x5d5c0780c302 - <std[f92b4c606f291077]::thread::lifecycle::spawn_unchecked<test[20e1f0ae6cad7a17]::run_test::{closure#1}, ()>::{closure#1} as core[786f478f706679df]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   43:     0x5d5c079a82bf - <alloc[64763625b5a07cdb]::boxed::Box<dyn core[786f478f706679df]::ops::function::FnOnce<(), Output = ()> + core[786f478f706679df]::marker::Send> as core[786f478f706679df]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/alloc/src/boxed.rs:2240:9
[INFO] [stdout]   44:     0x5d5c079a82bf - <std[f92b4c606f291077]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/sys/thread/unix.rs:118:17
[INFO] [stdout]   45:     0x7745036b4aa4 - <unknown>
[INFO] [stdout]   46:     0x774503741a64 - clone
[INFO] [stdout]   47:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- tests::test_with_microphone stdout ----
[INFO] [stdout] Ok(DeviceDescription { name: "Default Audio Device", manufacturer: None, driver: Some("default"), device_type: Unknown, interface_type: Unknown, direction: Unknown, address: None, extended: ["Default Audio Device"] })
[INFO] [stdout] 
[INFO] [stdout] thread 'tests::test_with_microphone' (19) panicked at src/lib.rs:71:64:
[INFO] [stdout] Failed to get device config.: DeviceNotAvailable
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5d5c079a89ea - std[f92b4c606f291077]::backtrace_rs::backtrace::libunwind::trace
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x5d5c079a89ea - std[f92b4c606f291077]::backtrace_rs::backtrace::trace_unsynchronized::<std[f92b4c606f291077]::sys::backtrace::_print_fmt::{closure#1}>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x5d5c079a89ea - std[f92b4c606f291077]::sys::backtrace::_print_fmt
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x5d5c079a89ea - <<std[f92b4c606f291077]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[786f478f706679df]::fmt::Display>::fmt
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x5d5c079be3ea - <core[786f478f706679df]::fmt::rt::Argument>::fmt
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x5d5c079be3ea - core[786f478f706679df]::fmt::write
[INFO] [stdout]    6:     0x5d5c079ad6e2 - std[f92b4c606f291077]::io::default_write_fmt::<alloc[64763625b5a07cdb]::vec::Vec<u8>>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/io/mod.rs:639:11
[INFO] [stdout]    7:     0x5d5c079ad6e2 - <alloc[64763625b5a07cdb]::vec::Vec<u8> as std[f92b4c606f291077]::io::Write>::write_fmt
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/io/mod.rs:1994:13
[INFO] [stdout]    8:     0x5d5c079870df - <std[f92b4c606f291077]::sys::backtrace::BacktraceLock>::print
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x5d5c079870df - std[f92b4c606f291077]::panicking::default_hook::{closure#0}
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panicking.rs:292:27
[INFO] [stdout]   10:     0x5d5c079a0b79 - std[f92b4c606f291077]::panicking::default_hook
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panicking.rs:316:9
[INFO] [stdout]   11:     0x5d5c07808c2c - <alloc[64763625b5a07cdb]::boxed::Box<dyn for<'a, 'b> core[786f478f706679df]::ops::function::Fn<(&'a std[f92b4c606f291077]::panic::PanicHookInfo<'b>,), Output = ()> + core[786f478f706679df]::marker::Sync + core[786f478f706679df]::marker::Send> as core[786f478f706679df]::ops::function::Fn<(&std[f92b4c606f291077]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/alloc/src/boxed.rs:2254:9
[INFO] [stdout]   12:     0x5d5c07808c2c - test[20e1f0ae6cad7a17]::test_main_with_exit_callback::<test[20e1f0ae6cad7a17]::test_main::{closure#0}>::{closure#0}
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/test/src/lib.rs:145:21
[INFO] [stdout]   13:     0x5d5c079a0df2 - <alloc[64763625b5a07cdb]::boxed::Box<dyn for<'a, 'b> core[786f478f706679df]::ops::function::Fn<(&'a std[f92b4c606f291077]::panic::PanicHookInfo<'b>,), Output = ()> + core[786f478f706679df]::marker::Sync + core[786f478f706679df]::marker::Send> as core[786f478f706679df]::ops::function::Fn<(&std[f92b4c606f291077]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/alloc/src/boxed.rs:2254:9
[INFO] [stdout]   14:     0x5d5c079a0df2 - std[f92b4c606f291077]::panicking::panic_with_hook
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panicking.rs:833:13
[INFO] [stdout]   15:     0x5d5c07987198 - std[f92b4c606f291077]::panicking::panic_handler::{closure#0}
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panicking.rs:698:13
[INFO] [stdout]   16:     0x5d5c0797ea79 - std[f92b4c606f291077]::sys::backtrace::__rust_end_short_backtrace::<std[f92b4c606f291077]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x5d5c07987ead - __rustc[8241495c18a89d70]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panicking.rs:689:5
[INFO] [stdout]   18:     0x5d5c079bebac - core[786f478f706679df]::panicking::panic_fmt
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x5d5c079be922 - core[786f478f706679df]::result::unwrap_failed
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/core/src/result.rs:1867:5
[INFO] [stdout]   20:     0x5d5c077a68ff - <core[786f478f706679df]::result::Result<cpal[98cfb9618284200c]::SupportedStreamConfig, cpal[98cfb9618284200c]::error::DefaultStreamConfigError>>::expect
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/core/src/result.rs:1185:23
[INFO] [stdout]   21:     0x5d5c07789857 - bitstream_autocorrelation[e90cdf0f6dfdf548]::tests::test_with_microphone::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/src/lib.rs:71:64
[INFO] [stdout]   22:     0x5d5c077912c2 - <core[786f478f706679df]::pin::Pin<&mut dyn core[786f478f706679df]::future::future::Future<Output = ()>> as core[786f478f706679df]::future::future::Future>::poll
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/core/src/future/future.rs:133:9
[INFO] [stdout]   23:     0x5d5c0775f25d - <tokio[3b93e57937491265]::runtime::park::CachedParkThread>::block_on::<core[786f478f706679df]::pin::Pin<&mut dyn core[786f478f706679df]::future::future::Future<Output = ()>>>::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.49.0/src/runtime/park.rs:284:71
[INFO] [stdout]   24:     0x5d5c0775c5c2 - tokio[3b93e57937491265]::task::coop::with_budget::<core[786f478f706679df]::task::poll::Poll<()>, <tokio[3b93e57937491265]::runtime::park::CachedParkThread>::block_on<core[786f478f706679df]::pin::Pin<&mut dyn core[786f478f706679df]::future::future::Future<Output = ()>>>::{closure#0}>
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.49.0/src/task/coop/mod.rs:167:5
[INFO] [stdout]   25:     0x5d5c0775c5c2 - tokio[3b93e57937491265]::task::coop::budget::<core[786f478f706679df]::task::poll::Poll<()>, <tokio[3b93e57937491265]::runtime::park::CachedParkThread>::block_on<core[786f478f706679df]::pin::Pin<&mut dyn core[786f478f706679df]::future::future::Future<Output = ()>>>::{closure#0}>
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.49.0/src/task/coop/mod.rs:133:5
[INFO] [stdout]   26:     0x5d5c0775c5c2 - <tokio[3b93e57937491265]::runtime::park::CachedParkThread>::block_on::<core[786f478f706679df]::pin::Pin<&mut dyn core[786f478f706679df]::future::future::Future<Output = ()>>>
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.49.0/src/runtime/park.rs:284:31
[INFO] [stdout]   27:     0x5d5c07780544 - <tokio[3b93e57937491265]::runtime::context::blocking::BlockingRegionGuard>::block_on::<core[786f478f706679df]::pin::Pin<&mut dyn core[786f478f706679df]::future::future::Future<Output = ()>>>
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.49.0/src/runtime/context/blocking.rs:66:14
[INFO] [stdout]   28:     0x5d5c077b7fb8 - <tokio[3b93e57937491265]::runtime::scheduler::multi_thread::MultiThread>::block_on::<core[786f478f706679df]::pin::Pin<&mut dyn core[786f478f706679df]::future::future::Future<Output = ()>>>::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.49.0/src/runtime/scheduler/multi_thread/mod.rs:89:22
[INFO] [stdout]   29:     0x5d5c07798f1b - tokio[3b93e57937491265]::runtime::context::runtime::enter_runtime::<<tokio[3b93e57937491265]::runtime::scheduler::multi_thread::MultiThread>::block_on<core[786f478f706679df]::pin::Pin<&mut dyn core[786f478f706679df]::future::future::Future<Output = ()>>>::{closure#0}, ()>
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.49.0/src/runtime/context/runtime.rs:65:16
[INFO] [stdout]   30:     0x5d5c077b6984 - <tokio[3b93e57937491265]::runtime::scheduler::multi_thread::MultiThread>::block_on::<core[786f478f706679df]::pin::Pin<&mut dyn core[786f478f706679df]::future::future::Future<Output = ()>>>
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.49.0/src/runtime/scheduler/multi_thread/mod.rs:88:9
[INFO] [stdout]   31:     0x5d5c07791da4 - <tokio[3b93e57937491265]::runtime::runtime::Runtime>::block_on_inner::<core[786f478f706679df]::pin::Pin<&mut dyn core[786f478f706679df]::future::future::Future<Output = ()>>>
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.49.0/src/runtime/runtime.rs:370:50
[INFO] [stdout]   32:     0x5d5c07791f9f - <tokio[3b93e57937491265]::runtime::runtime::Runtime>::block_on::<core[786f478f706679df]::pin::Pin<&mut dyn core[786f478f706679df]::future::future::Future<Output = ()>>>
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.49.0/src/runtime/runtime.rs:342:18
[INFO] [stdout]   33:     0x5d5c0778e0b3 - bitstream_autocorrelation[e90cdf0f6dfdf548]::tests::test_with_microphone
[INFO] [stdout]                                at /opt/rustwide/workdir/src/lib.rs:120:27
[INFO] [stdout]   34:     0x5d5c07789447 - bitstream_autocorrelation[e90cdf0f6dfdf548]::tests::test_with_microphone::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/src/lib.rs:67:36
[INFO] [stdout]   35:     0x5d5c077560d6 - <bitstream_autocorrelation[e90cdf0f6dfdf548]::tests::test_with_microphone::{closure#0} as core[786f478f706679df]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   36:     0x5d5c077fcd0b - <fn() -> core[786f478f706679df]::result::Result<(), alloc[64763625b5a07cdb]::string::String> as core[786f478f706679df]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   37:     0x5d5c077fcd0b - test[20e1f0ae6cad7a17]::__rust_begin_short_backtrace::<core[786f478f706679df]::result::Result<(), alloc[64763625b5a07cdb]::string::String>, fn() -> core[786f478f706679df]::result::Result<(), alloc[64763625b5a07cdb]::string::String>>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/test/src/lib.rs:663:18
[INFO] [stdout]   38:     0x5d5c078096fb - test[20e1f0ae6cad7a17]::run_test_in_process::{closure#0}
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/test/src/lib.rs:686:74
[INFO] [stdout]   39:     0x5d5c078096fb - <core[786f478f706679df]::panic::unwind_safe::AssertUnwindSafe<test[20e1f0ae6cad7a17]::run_test_in_process::{closure#0}> as core[786f478f706679df]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   40:     0x5d5c078096fb - std[f92b4c606f291077]::panicking::catch_unwind::do_call::<core[786f478f706679df]::panic::unwind_safe::AssertUnwindSafe<test[20e1f0ae6cad7a17]::run_test_in_process::{closure#0}>, core[786f478f706679df]::result::Result<(), alloc[64763625b5a07cdb]::string::String>>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panicking.rs:581:40
[INFO] [stdout]   41:     0x5d5c078096fb - std[f92b4c606f291077]::panicking::catch_unwind::<core[786f478f706679df]::result::Result<(), alloc[64763625b5a07cdb]::string::String>, core[786f478f706679df]::panic::unwind_safe::AssertUnwindSafe<test[20e1f0ae6cad7a17]::run_test_in_process::{closure#0}>>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panicking.rs:544:19
[INFO] [stdout]   42:     0x5d5c078096fb - std[f92b4c606f291077]::panic::catch_unwind::<core[786f478f706679df]::panic::unwind_safe::AssertUnwindSafe<test[20e1f0ae6cad7a17]::run_test_in_process::{closure#0}>, core[786f478f706679df]::result::Result<(), alloc[64763625b5a07cdb]::string::String>>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panic.rs:359:14
[INFO] [stdout]   43:     0x5d5c078096fb - test[20e1f0ae6cad7a17]::run_test_in_process
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/test/src/lib.rs:686:27
[INFO] [stdout]   44:     0x5d5c078096fb - test[20e1f0ae6cad7a17]::run_test::{closure#0}
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/test/src/lib.rs:607:43
[INFO] [stdout]   45:     0x5d5c07804e14 - test[20e1f0ae6cad7a17]::run_test::{closure#1}
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/test/src/lib.rs:637:41
[INFO] [stdout]   46:     0x5d5c07804e14 - std[f92b4c606f291077]::sys::backtrace::__rust_begin_short_backtrace::<test[20e1f0ae6cad7a17]::run_test::{closure#1}, ()>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   47:     0x5d5c0780c302 - std[f92b4c606f291077]::thread::lifecycle::spawn_unchecked::<test[20e1f0ae6cad7a17]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/thread/lifecycle.rs:91:13
[INFO] [stdout]   48:     0x5d5c0780c302 - <core[786f478f706679df]::panic::unwind_safe::AssertUnwindSafe<std[f92b4c606f291077]::thread::lifecycle::spawn_unchecked<test[20e1f0ae6cad7a17]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}> as core[786f478f706679df]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   49:     0x5d5c0780c302 - std[f92b4c606f291077]::panicking::catch_unwind::do_call::<core[786f478f706679df]::panic::unwind_safe::AssertUnwindSafe<std[f92b4c606f291077]::thread::lifecycle::spawn_unchecked<test[20e1f0ae6cad7a17]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panicking.rs:581:40
[INFO] [stdout]   50:     0x5d5c0780c302 - std[f92b4c606f291077]::panicking::catch_unwind::<(), core[786f478f706679df]::panic::unwind_safe::AssertUnwindSafe<std[f92b4c606f291077]::thread::lifecycle::spawn_unchecked<test[20e1f0ae6cad7a17]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panicking.rs:544:19
[INFO] [stdout]   51:     0x5d5c0780c302 - std[f92b4c606f291077]::panic::catch_unwind::<core[786f478f706679df]::panic::unwind_safe::AssertUnwindSafe<std[f92b4c606f291077]::thread::lifecycle::spawn_unchecked<test[20e1f0ae6cad7a17]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panic.rs:359:14
[INFO] [stdout]   52:     0x5d5c0780c302 - std[f92b4c606f291077]::thread::lifecycle::spawn_unchecked::<test[20e1f0ae6cad7a17]::run_test::{closure#1}, ()>::{closure#1}
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/thread/lifecycle.rs:89:26
[INFO] [stdout]   53:     0x5d5c0780c302 - <std[f92b4c606f291077]::thread::lifecycle::spawn_unchecked<test[20e1f0ae6cad7a17]::run_test::{closure#1}, ()>::{closure#1} as core[786f478f706679df]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   54:     0x5d5c079a82bf - <alloc[64763625b5a07cdb]::boxed::Box<dyn core[786f478f706679df]::ops::function::FnOnce<(), Output = ()> + core[786f478f706679df]::marker::Send> as core[786f478f706679df]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/alloc/src/boxed.rs:2240:9
[INFO] [stdout]   55:     0x5d5c079a82bf - <std[f92b4c606f291077]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/sys/thread/unix.rs:118:17
[INFO] [stdout]   56:     0x7745036b4aa4 - <unknown>
[INFO] [stdout]   57:     0x774503741a64 - clone
[INFO] [stdout]   58:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout]     tests::test_from_files
[INFO] [stdout]     tests::test_with_microphone
[INFO] [stdout] 
[INFO] [stdout] test result: FAILED. 1 passed; 2 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.20s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "478f21d14ea9643afc368f900808fc5bea048e16f188197fc0c5fc8b6930b48b", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "478f21d14ea9643afc368f900808fc5bea048e16f188197fc0c5fc8b6930b48b", kill_on_drop: false }`
[INFO] [stdout] 478f21d14ea9643afc368f900808fc5bea048e16f188197fc0c5fc8b6930b48b
